[INFO] fetching crate jupyter-protocol 1.4.0...
[INFO] testing jupyter-protocol-1.4.0 against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065-1
[INFO] extracting crate jupyter-protocol 1.4.0 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate jupyter-protocol 1.4.0
[INFO] finished tweaking crates.io crate jupyter-protocol 1.4.0
[INFO] tweaked toml for crates.io crate jupyter-protocol 1.4.0 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate jupyter-protocol 1.4.0 on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate jupyter-protocol 1.4.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5870caa3b5b09186343d8bc335c5812af5a4e5eb736ce92f35795421d653c3ad
[INFO] running `Command { std: "docker" "start" "-a" "5870caa3b5b09186343d8bc335c5812af5a4e5eb736ce92f35795421d653c3ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5870caa3b5b09186343d8bc335c5812af5a4e5eb736ce92f35795421d653c3ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5870caa3b5b09186343d8bc335c5812af5a4e5eb736ce92f35795421d653c3ad", kill_on_drop: false }`
[INFO] [stdout] 5870caa3b5b09186343d8bc335c5812af5a4e5eb736ce92f35795421d653c3ad
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e6a24ee5c6bfc14d982f84e05d8243e76b8dab4b8258614fadfd3bf4d450a170
[INFO] running `Command { std: "docker" "start" "-a" "e6a24ee5c6bfc14d982f84e05d8243e76b8dab4b8258614fadfd3bf4d450a170", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling zmij v1.0.19
[INFO] [stderr]    Compiling sha1_smol v1.0.1
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling uuid v1.20.0
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling jupyter-protocol v1.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.15s
[INFO] running `Command { std: "docker" "inspect" "e6a24ee5c6bfc14d982f84e05d8243e76b8dab4b8258614fadfd3bf4d450a170", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e6a24ee5c6bfc14d982f84e05d8243e76b8dab4b8258614fadfd3bf4d450a170", kill_on_drop: false }`
[INFO] [stdout] e6a24ee5c6bfc14d982f84e05d8243e76b8dab4b8258614fadfd3bf4d450a170
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 36b1bccf571233cb83a72d678ef5c50f535d0fe3821dc1a31a3b6808df456075
[INFO] running `Command { std: "docker" "start" "-a" "36b1bccf571233cb83a72d678ef5c50f535d0fe3821dc1a31a3b6808df456075", kill_on_drop: false }`
[INFO] [stderr]    Compiling jupyter-protocol v1.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 5.12s
[INFO] running `Command { std: "docker" "inspect" "36b1bccf571233cb83a72d678ef5c50f535d0fe3821dc1a31a3b6808df456075", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "36b1bccf571233cb83a72d678ef5c50f535d0fe3821dc1a31a3b6808df456075", kill_on_drop: false }`
[INFO] [stdout] 36b1bccf571233cb83a72d678ef5c50f535d0fe3821dc1a31a3b6808df456075
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] aa163a73b8b3012ba10e0136861d79a1460bc9f85e80571d6b2c5842d9f74252
[INFO] running `Command { std: "docker" "start" "-a" "aa163a73b8b3012ba10e0136861d79a1460bc9f85e80571d6b2c5842d9f74252", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/jupyter_protocol-926e2f6462c56794)
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test connection_info::test::test_connection_info_urls ... ok
[INFO] [stdout] test connection_info::test::test_parse_connection_info ... ok
[INFO] [stdout] test media::datatable::tests::test_deserialize_minimal_datatable ... ok
[INFO] [stdout] test media::datatable::tests::test_deserialize_comprensive_datatable ... ok
[INFO] [stdout] test media::test::deserialize_json_media_type ... ok
[INFO] [stdout] test media::test::deserialize_unknown_json_media_type ... ok
[INFO] [stdout] test media::test::find_nothing_and_be_happy ... ok
[INFO] [stdout] test media::test::find_table ... ok
[INFO] [stdout] test media::test::ensure_array_of_text_processed ... ok
[INFO] [stdout] test media::test::no_media_type_supported ... ok
[INFO] [stdout] test media::test::svg_array_deserialized_correctly ... ok
[INFO] [stdout] test messaging::test::test_default ... ok
[INFO] [stdout] test media::test::richest_middle ... ok
[INFO] [stdout] test messaging::test::test_enum_variant_sizes ... ok
[INFO] [stdout] test messaging::test::test_execute_reply_without_execution_count ... ok
[INFO] [stdout] test messaging::test::test_deserialize_jupyter_message ... ok
[INFO] [stdout] test media::test::svg_deserialized_correctly ... ok
[INFO] [stdout] test messaging::test::test_deserialize_payload ... ok
[INFO] [stdout] test messaging::test::test_execute_reply_without_user_expressions ... ok
[INFO] [stdout] test messaging::test::test_execute_request_user_expressions_serializes_to_empty_dict ... ok
[INFO] [stdout] test messaging::test::test_display_data_various_data ... ok
[INFO] [stdout] test messaging::test::test_execute_reply_user_expressions_deserialization ... ok
[INFO] [stdout] test messaging::test::test_header_missing_date_defaults_to_epoch ... ok
[INFO] [stdout] test messaging::test::test_jupyter_message_content_enum_size ... ok
[INFO] [stdout] test messaging::test::test_jupyter_message_empty_parent_header_deserialize ... ok
[INFO] [stdout] test messaging::test::test_header_with_date_parses_correctly ... ok
[INFO] [stdout] test messaging::test::test_jupyter_message_parent_header_serializes_to_empty_dict ... ok
[INFO] [stdout] test messaging::test::test_jupyter_message_parent_header_deserialize ... ok
[INFO] [stdout] test messaging::test::test_execute_request_serialize ... ok
[INFO] [stdout] test messaging::test::test_iopub_welcome_message ... ok
[INFO] [stdout] test messaging::test::test_execution_state_other_serde ... ok
[INFO] [stdout] test messaging::test::test_into_various ... ok
[INFO] [stdout] test messaging::test::test_kernel_info_reply_missing_status_defaults_to_ok ... ok
[INFO] [stdout] test messaging::test::test_user_expressions_serialization ... ok
[INFO] [stdout] test messaging::test::test_kernel_info_reply_with_status_parses_correctly ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests jupyter_protocol
[INFO] [stdout] 
[INFO] [stdout] running 52 tests
[INFO] [stdout] test src/messaging.rs - messaging::Channel (line 79) ... ok
[INFO] [stdout] test src/execution_count.rs - execution_count (line 10) ... ok
[INFO] [stdout] test src/connection_info.rs - connection_info (line 22) ... ok
[INFO] [stdout] test src/connection_info.rs - connection_info::ConnectionInfo (line 82) ... ok
[INFO] [stdout] test src/messaging.rs - messaging (line 35) ... ok
[INFO] [stdout] test src/media/mod.rs - media (line 16) ... ok
[INFO] [stdout] test src/messaging.rs - messaging (line 23) ... ok
[INFO] [stdout] test src/lib.rs - (line 20) ... ok
[INFO] [stdout] test src/kernelspec.rs - kernelspec::JupyterKernelspec (line 37) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::CommClose::as_child_of (line 734) ... ok
[INFO] [stdout] test src/media/mod.rs - media (line 27) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::CommInfoRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::CommInfoReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::CommOpen::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::ClearOutput::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::DebugRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/media/mod.rs - media::Media::richest (line 364) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::CommMsg::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::DisplayData::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::ExecuteRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::CompleteReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::ExecuteInput::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::DisplayData (line 1240) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::DebugReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::ExecuteResult::as_child_of (line 734) ... ok
[INFO] [stdout] test src/kernelspec.rs - kernelspec (line 12) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::CompleteRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::ExecuteReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::Header (line 135) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::ErrorOutput::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::HistoryReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::InputRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::InspectRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::HistoryRequest::as_child_of (line 798) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::InterruptReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::InspectReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::IsCompleteRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::JupyterMessage (line 258) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::JupyterMessage (line 239) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::InputReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::KernelInfoRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::ShutdownRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::InterruptRequest::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::IoPubWelcome::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::IsCompleteReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::StreamContent (line 1161) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::Status::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::ShutdownReply::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::UnknownMessage::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::StreamContent::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::UpdateDisplayData::as_child_of (line 734) ... ok
[INFO] [stdout] test src/messaging.rs - messaging::UnknownMessage (line 842) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.98s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "aa163a73b8b3012ba10e0136861d79a1460bc9f85e80571d6b2c5842d9f74252", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aa163a73b8b3012ba10e0136861d79a1460bc9f85e80571d6b2c5842d9f74252", kill_on_drop: false }`
[INFO] [stdout] aa163a73b8b3012ba10e0136861d79a1460bc9f85e80571d6b2c5842d9f74252
